[INFO] cloning repository https://github.com/GeyzsoN/prosperity_rust_backtester
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/GeyzsoN/prosperity_rust_backtester" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FGeyzsoN%2Fprosperity_rust_backtester", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FGeyzsoN%2Fprosperity_rust_backtester'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3997c21b1f5f7984f83c5714654e80d895984dbf
[INFO] testing GeyzsoN/prosperity_rust_backtester against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FGeyzsoN%2Fprosperity_rust_backtester" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/GeyzsoN/prosperity_rust_backtester
[INFO] finished tweaking git repo https://github.com/GeyzsoN/prosperity_rust_backtester
[INFO] tweaked toml for git repo https://github.com/GeyzsoN/prosperity_rust_backtester written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/GeyzsoN/prosperity_rust_backtester on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/GeyzsoN/prosperity_rust_backtester already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c2069aac21281b3561a6c0449c0b5a8deb676ebc387e4519e62c4ca4d762c4a0
[INFO] running `Command { std: "docker" "start" "-a" "c2069aac21281b3561a6c0449c0b5a8deb676ebc387e4519e62c4ca4d762c4a0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c2069aac21281b3561a6c0449c0b5a8deb676ebc387e4519e62c4ca4d762c4a0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c2069aac21281b3561a6c0449c0b5a8deb676ebc387e4519e62c4ca4d762c4a0", kill_on_drop: false }`
[INFO] [stdout] c2069aac21281b3561a6c0449c0b5a8deb676ebc387e4519e62c4ca4d762c4a0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ebb71141ebfaf9b0b24fe9e3a0085045c82a8265834987e76e4134c9be27ea83
[INFO] running `Command { std: "docker" "start" "-a" "ebb71141ebfaf9b0b24fe9e3a0085045c82a8265834987e76e4134c9be27ea83", kill_on_drop: false }`
[INFO] [stderr]    Compiling target-lexicon v0.13.5
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling memoffset v0.9.1
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling indoc v2.0.7
[INFO] [stderr]    Compiling unindent v0.2.4
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling pyo3-build-config v0.27.2
[INFO] [stderr]    Compiling pyo3-ffi v0.27.2
[INFO] [stderr]    Compiling pyo3-macros-backend v0.27.2
[INFO] [stderr]    Compiling pyo3 v0.27.2
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling pyo3-macros v0.27.2
[INFO] [stderr]    Compiling rust_backtester v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.49s
[INFO] running `Command { std: "docker" "inspect" "ebb71141ebfaf9b0b24fe9e3a0085045c82a8265834987e76e4134c9be27ea83", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ebb71141ebfaf9b0b24fe9e3a0085045c82a8265834987e76e4134c9be27ea83", kill_on_drop: false }`
[INFO] [stdout] ebb71141ebfaf9b0b24fe9e3a0085045c82a8265834987e76e4134c9be27ea83
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9c3d871a04bc8e9f348201c55480275e6d96876042e985da8fa28437269501fb
[INFO] running `Command { std: "docker" "start" "-a" "9c3d871a04bc8e9f348201c55480275e6d96876042e985da8fa28437269501fb", kill_on_drop: false }`
[INFO] [stderr]    Compiling rust_backtester v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.59s
[INFO] running `Command { std: "docker" "inspect" "9c3d871a04bc8e9f348201c55480275e6d96876042e985da8fa28437269501fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9c3d871a04bc8e9f348201c55480275e6d96876042e985da8fa28437269501fb", kill_on_drop: false }`
[INFO] [stdout] 9c3d871a04bc8e9f348201c55480275e6d96876042e985da8fa28437269501fb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 44919cf27b8418dc6f68d6e56f0453de6cf9f60ec16b4e86cc94788c8e9b849e
[INFO] running `Command { std: "docker" "start" "-a" "44919cf27b8418dc6f68d6e56f0453de6cf9f60ec16b4e86cc94788c8e9b849e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rust_backtester-589e7f7cd54c3a7f)
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stdout] test cli::tests::dataset_alias_defaults_to_latest_round ... ok
[INFO] [stdout] test cli::tests::merged_submission_log_combines_rows_without_repeating_header ... ok
[INFO] [stdout] test cli::tests::product_split_adds_total_column_for_multi_run_output ... ok
[INFO] [stdout] test cli::tests::product_split_formats_compact_table ... ok
[INFO] [stdout] test cli::tests::product_display_defaults_to_full ... ok
[INFO] [stdout] test cli::tests::product_split_off_hides_table ... ok
[INFO] [stdout] test cli::tests::product_split_full_keeps_long_lists_unrolled ... ok
[INFO] [stdout] test cli::tests::product_split_summarizes_long_lists ... ok
[INFO] [stdout] test cli::tests::run_suffix_distinguishes_negative_and_positive_days ... ok
[INFO] [stdout] test cli::tests::run_suffix_includes_dataset_and_day ... ok
[INFO] [stdout] test cli::tests::run_suffix_includes_round_for_submission_logs ... ok
[INFO] [stdout] test cli::tests::short_label_formats_positive_days_with_plus ... ok
[INFO] [stdout] test cli::tests::short_label_uses_known_aliases ... ok
[INFO] [stdout] test cli::tests::short_label_formats_day_zero_consistently ... ok
[INFO] [stdout] test cli::tests::collect_dataset_files_ignores_unrelated_log_files ... ok
[INFO] [stdout] test model::tests::missing_paired_trades_csv_is_an_error ... ok
[INFO] [stdout] test cli::tests::explicit_dataset_path_does_not_require_populated_default_datasets_root ... ok
[INFO] [stdout] test runner::tests::market_trade_duplicate_filter_skips_touch_submission_rows ... ok
[INFO] [stdout] test runner::tests::display_path_prefers_project_relative_paths ... ok
[INFO] [stdout] test cli::tests::collect_dataset_files_materializes_submission_json_from_log ... ok
[INFO] [stdout] test cli::tests::round_submission_entry_uses_generated_submission_json ... ok
[INFO] [stdout] test model::tests::paired_observations_csv_populates_conversion_observations ... ok
[INFO] [stdout] test runner::tests::non_csv_trade_history_replay_keeps_queue_penetration_behavior ... ok
[INFO] [stdout] test model::tests::submission_trade_history_uses_day_when_present ... ok
[INFO] [stdout] test runner::tests::product_specific_limits_allow_positions_up_to_cap ... ok
[INFO] [stdout] test runner::tests::product_specific_limits_reject_orders_beyond_cap ... ok
[INFO] [stdout] test runner::tests::queue_penetration_uses_bankers_rounding ... ok
[INFO] [stdout] test runner::tests::python_round_helpers_work ... ok
[INFO] [stdout] test runner::tests::raw_csv_visible_ask_can_fully_block_submission_ask_fill ... ok
[INFO] [stdout] test runner::tests::raw_csv_visible_bid_can_fully_block_submission_bid_fill ... ok
[INFO] [stdout] test runner::tests::raw_csv_same_price_priority_prefers_visible_book_before_submission_remainder ... ok
[INFO] [stdout] test runner::tests::round3_products_use_wiki_position_limits ... ok
[INFO] [stdout] test runner::tests::round5_products_use_limit_ten ... ok
[INFO] [stdout] test runner::tests::same_price_market_trade_respects_visible_queue_ahead ... ok
[INFO] [stdout] test runner::tests::slippage_adjustment_matches_expected_rounding ... ok
[INFO] [stdout] test runner::tests::trade_match_modes_follow_python_logic ... ok
[INFO] [stdout] test runner::tests::consumed_market_trade_is_removed_from_bundle_timeline ... ok
[INFO] [stdout] test runner::tests::dataset_override_carries_position_across_days ... ok
[INFO] [stdout] test runner::tests::empty_book_carries_forward_last_mark_for_pnl_and_activity_log ... ok
[INFO] [stdout] test runner::tests::first_one_sided_tick_bootstraps_mark_from_visible_side ... ok
[INFO] [stdout] test runner::tests::one_sided_book_carries_forward_last_stable_mid ... ok
[INFO] [stdout] test runner::tests::raw_csv_submission_crosses_book_then_resting_order_is_hit_by_tape ... ok
[INFO] [stdout] test runner::tests::raw_csv_residual_public_tape_is_carried_to_next_tick_and_logged ... ok
[INFO] [stdout] test cli::tests::tutorial_dataset_returns_single_day ... ok
[INFO] [stdout] test cli::tests::carry_dataset_normalizes_day_boundaries_into_continuous_timestamps ... ok
[INFO] [stdout] test cli::tests::carry_plan_groups_tutorial_days_but_leaves_submission_separate ... ok
[INFO] [stdout] test runner::tests::log_only_mode_writes_submission_log_and_metrics ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.82s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rust_backtester-5cd424613d350378)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rust_backtester
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "44919cf27b8418dc6f68d6e56f0453de6cf9f60ec16b4e86cc94788c8e9b849e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "44919cf27b8418dc6f68d6e56f0453de6cf9f60ec16b4e86cc94788c8e9b849e", kill_on_drop: false }`
[INFO] [stdout] 44919cf27b8418dc6f68d6e56f0453de6cf9f60ec16b4e86cc94788c8e9b849e
